[08/13 12:30:52,Telerik.TestStudio.exe(1460:1),Uncategorized] Orchestrator._iUIProject_TestSelected() : Test 'WebTest' selected.
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:30:55,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:30:56,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:30:56,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:30:56,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25)] First trace message from pool thread "Remoted async command listener" (managed ID = 25, native ID = 2224).
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25)] First trace message from pool thread "EnsureActiveBrowser worker" (managed ID = 25, native ID = 2224).
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=5952, Path="C:\Program Files (x86)\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=527774)...
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] Connector.Start() : Process launched (ID=4540, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 984720").
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] Connector.Start() : Process exited (ID=4540, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 984720").
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio" (ID=1460) is assumed to host the controller.
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] Connector.InjectCode() : ------- Function Start -------
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] Connector.InjectCode() : Connection string: C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.2.1527.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?1460
[08/13 12:31:00,Telerik.TestStudio.exe(1460:25),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984720 on another thread...
[08/13 12:31:00,Telerik.TestStudio.exe(1460:76)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 76, native ID = 5592).
[08/13 12:31:00,Telerik.TestStudio.exe(1460:76),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[08/13 12:31:01,Telerik.TestStudio.exe(1460:25),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:31:01,Telerik.TestStudio.exe(1460:25),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 984720 (lpData = "C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.2.1527.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?1460")...
[08/13 12:31:26,iexplore.exe(4592:1)] First trace message from process 4592: "C:\Program Files (x86)\Internet Explorer\iexplore.exe" SCODEF:5952 CREDAT:145409
[08/13 12:31:26,iexplore.exe(4592:1)] First trace message from background thread "ArtOfTestPluginEntryPoint entry point thread" (managed ID = 1, native ID = 5840).
[08/13 12:31:26,iexplore.exe(4592:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 984720, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-1396743285", PID = 1460).
[08/13 12:31:27,iexplore.exe(4592:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984720 on same thread...
[08/13 12:31:27,iexplore.exe(4592:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:31:27,iexplore.exe(4592:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_c0d05290-5238-4f9f-979c-4b31375c54d1".
[08/13 12:31:27,Telerik.TestStudio.exe(1460:14),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[08/13 12:31:27,Telerik.TestStudio.exe(1460:18)] First trace message from background thread "Remoted async command listener" (managed ID = 18, native ID = 7164).
[08/13 12:31:27,Telerik.TestStudio.exe(1460:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[08/13 12:31:27,iexplore.exe(4592:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "c87a276c-e664-47f3-9e29-77998c60ef15.CommandPipe", Async = "c87a276c-e664-47f3-9e29-77998c60ef15.AsyncPipe"}
[08/13 12:31:27,Telerik.TestStudio.exe(1460:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[08/13 12:31:27,Telerik.TestStudio.exe(1460:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[08/13 12:31:27,Telerik.TestStudio.exe(1460:14),Framework] Manager.AddNewBrowser() : Added client ID "Client_c0d05290-5238-4f9f-979c-4b31375c54d1" (now there is/are 1 total).
[08/13 12:31:27,Telerik.TestStudio.exe(1460:25),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[08/13 12:31:27,Telerik.TestStudio.exe(1460:25),Framework] Connector.InjectCode() : ------- Function End -------
[08/13 12:31:27,Telerik.TestStudio.exe(1460:35)] First trace message from foreground thread "AttachRecorderToWindow thread" (managed ID = 35, native ID = 6664).
[08/13 12:31:27,Telerik.TestStudio.exe(1460:35),Framework] Connector.Start() : Process launched (ID=4268, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 984720").
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] Connector.Start() : Process exited (ID=4268, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 984720").
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] Connector.InjectCode() : ------- Function Start -------
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] Connector.InjectCode() : Connection string: C:\Windows\assembly\GAC_MSIL\ArtOfTest.WebAii.Design.RemoteRecorder\2012.2.1527.0__56fa9668d21d4722\ArtOfTest.WebAii.Design.RemoteRecorder.dll?ArtOfTest.WebAii.Design.RemoteRecorder.RemotedRecorderEntryPoint?1460
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984720 on another thread...
[08/13 12:31:28,Telerik.TestStudio.exe(1460:7)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 7, native ID = 4204).
[08/13 12:31:28,Telerik.TestStudio.exe(1460:7),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:31:28,Telerik.TestStudio.exe(1460:35),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 984720 (lpData = "C:\Windows\assembly\GAC_MSIL\ArtOfTest.WebAii.Design.RemoteRecorder\2012.2.1527.0__56fa9668d21d4722\ArtOfTest.WebAii.Design.RemoteRecorder.dll?ArtOfTest.WebAii.Design.RemoteRecorder.RemotedRecorderEntryPoint?1460")...
[08/13 12:31:28,iexplore.exe(4592:1)] First trace message from background thread "RemotedRecorderEntryPoint entry point thread" (managed ID = 1, native ID = 5840).
[08/13 12:31:28,iexplore.exe(4592:1),Recording] RemotedRecorderEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (hwndString "984720:Pipe.ArtOfTest.WebAii.BrowserProvisioner_-1396743285:1460" as Remoted).
[08/13 12:31:31,iexplore.exe(4592:8)] First trace message from background thread "ConnectingSurfaceThread For HWND 984720" (managed ID = 8, native ID = 6264).
[08/13 12:31:31,iexplore.exe(4592:8),Recording] <>c__DisplayClass4.<CreateConnectingSurface>b__0() : ConnectingSurface displayed upon parent HWND 984720.
[08/13 12:31:32,iexplore.exe(4592:1),Recording] RemoteRecorder constructor : Set NetNamedPipeBinding successful.
[08/13 12:31:32,iexplore.exe(4592:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984720 on same thread...
[08/13 12:31:32,iexplore.exe(4592:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:31:32,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Loading Translator Groups
[08/13 12:31:32,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[08/13 12:31:32,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[08/13 12:31:33,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[08/13 12:31:33,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Loading Custom Silverlight Types
[08/13 12:31:33,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Registering Silverlight Mime Filter...
[08/13 12:31:33,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Succesfully requested mime filter registration
[08/13 12:31:33,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Endpoint address will be: net.pipe://localhost/WebAiiDesignCavnas_11/Recorder/1460
[08/13 12:31:33,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Creating preliminary connection for type identification
[08/13 12:31:49,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Opening preliminary connection
[08/13 12:31:49,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Loading serializable types
[08/13 12:31:50,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Closing preliminary connection
[08/13 12:31:50,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Creating primary connection
[08/13 12:31:50,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Opening primary connection
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Enabling Host-Side Logging
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Disabling Warning Bar
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Locating WebBrowserClass
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Attaching to WebBrowserClass Events
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.SetSite() : Creating Embedded Window
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : ------- Function Start -------
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : Adding HWND 984720
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : Get UserSettings from host
[08/13 12:31:51,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : Create RSM
[08/13 12:31:52,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[08/13 12:31:52,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[08/13 12:31:52,iexplore.exe(4592:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : Call RSM.Bind
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function Start -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : DesignerBrowser is Ready. Attaching Events
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling AttachRecordingListener
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function Start -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Inside the (lock)
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Releasing HtmlDoc References (Count:0)
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Creating the (MAIN) document reference.
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Building (FRAMES) and references.
[08/13 12:31:53,iexplore.exe(4592:1),Uncategorized] IERecordingSurface.AttachRecordingListener() : _nativeRecorderWindow is null
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Attaching the keyboard events
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Starting the KeyBoard Recorder
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Keyboard Recorder Started
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function End -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.RefreshAndMapBrowsersAndFrames() : Calling RefreshDomTree
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Setting IsDomLoaded=true
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling InitializeSilverlightRecorder()
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function Start -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function Start -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function End -------
[08/13 12:31:53,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function End -------
[08/13 12:31:54,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:19)] First trace message from foreground thread "IENavigation Initializer" (managed ID = 19, native ID = 7016).
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.Initialize() : Attempting to detect missing buttons after half-second wait intervals...
[08/13 12:31:55,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : Call Host.RegisterInstance
[08/13 12:31:55,Telerik.TestStudio.exe(1460:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[08/13 12:31:55,Telerik.TestStudio.exe(1460:1),Framework] Manager.get_ActiveBrowser() : ActiveBrowser URL is ''
[08/13 12:31:55,Telerik.TestStudio.exe(1460:1),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[08/13 12:31:55,Telerik.TestStudio.exe(1460:1),Framework] Manager.get_ActiveBrowser() : ActiveBrowser URL is ''
[08/13 12:31:55,iexplore.exe(4592:1),Recording] RemoteRecorder.ie_DocumentComplete() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function Start -------
[08/13 12:31:55,Telerik.TestStudio.exe(1460:35),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[08/13 12:31:55,Telerik.TestStudio.exe(1460:35),Framework] Connector.InjectCode() : ------- Function End -------
[08/13 12:31:55,Telerik.TestStudio.exe(1460:35),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[08/13 12:31:55,Telerik.TestStudio.exe(1460:35),Framework] Manager.get_ActiveBrowser() : ActiveBrowser URL is ''
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : DesignerBrowser is Ready. Attaching Events
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling AttachRecordingListener
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function Start -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Inside the (lock)
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Releasing HtmlDoc References (Count:1)
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Creating the (MAIN) document reference.
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Building (FRAMES) and references.
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function End -------
[08/13 12:31:55,iexplore.exe(4592:1),Recording] IERecordingSurface.RefreshAndMapBrowsersAndFrames() : Calling RefreshDomTree
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Setting IsDomLoaded=true
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Invoking (Propagating the DocumentComplete event)
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function Start -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : EnableSurface
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ClearHighlights
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : If DomVisible Populate it
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : DOM is NOT Visible
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : RequestMatch called
[08/13 12:31:56,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling InitializeSilverlightRecorder()
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function Start -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function Start -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:56,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:57,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:58,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:31:59,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:32:00,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function Start -------
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Back
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Forward
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Stop (Esc)
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element Refresh (F5)
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.CheckAutomationElement() : Unable to find element (HWND Caption): Address Band Root
[08/13 12:32:01,iexplore.exe(4592:19),Recording] IENavigation.FindNavigationButtons() : ------- Function End -------
[08/13 12:32:01,iexplore.exe(4592:19),Error] IENavigation.Initialize() : Unable to detect buttons even after re-try!
[08/13 12:32:06,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function Start -------
[08/13 12:32:06,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function Start -------
[08/13 12:32:06,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function End -------
[08/13 12:32:06,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function Start -------
[08/13 12:32:06,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DownloadBegin() : ------- Function End -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function Start -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function End -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function Start -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Navigating() : ------- Function End -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function Start -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function Start -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : DesignerBrowser is Ready. Attaching Events
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling AttachRecordingListener
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function Start -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Inside the (lock)
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Releasing HtmlDoc References (Count:1)
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Creating the (MAIN) document reference.
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Building (FRAMES) and references.
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/jsp/content.jsp?sid=0&id=3&sid=0&RequestID=idsujUcgt.00zr360e3upQlo5tDOc&MajorVersion=1&MinorVersion=2&IssueInstant=2013-08-12T23%3A29%3A10Z&ProviderID=https%3A%2F%2Fag2e2ssl.dmp.wa.gov.au%3A443%2Fnesp%2Fidff%2Fmetadata&RelayState=Mg%3D%3D&consent=urn%3Aliberty%3Aconsent%3Aunavailable&ForceAuthn=false&IsPassive=false&NameIDPolicy=onetime&ProtocolProfile=http%3A%2F%2Fprojectliberty.org%2Fprofiles%2Fbrws-art&target=https%3A%2F%2Face.dmp.wa.gov.au%2FACE%2FSecurity%2FLogin%3FReturnUrl%3D%252face%252f&AuthnContextStatementRef=name%2Fpassword%2Furi
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/idff/sso?id=3&sid=0&option=credential&sid=0
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function End -------
[08/13 12:32:41,iexplore.exe(4592:1),Recording] IERecordingSurface.RefreshAndMapBrowsersAndFrames() : Calling RefreshDomTree
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Setting IsDomLoaded=true
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Invoking (Propagating the DocumentComplete event)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : EnableSurface
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ClearHighlights
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : If DomVisible Populate it
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : DOM is NOT Visible
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : RequestMatch called
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling InitializeSilverlightRecorder()
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : DesignerBrowser is Ready. Attaching Events
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling AttachRecordingListener
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Inside the (lock)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Releasing HtmlDoc References (Count:3)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Creating the (MAIN) document reference.
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Building (FRAMES) and references.
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/jsp/content.jsp?sid=0&id=3&sid=0&RequestID=idsujUcgt.00zr360e3upQlo5tDOc&MajorVersion=1&MinorVersion=2&IssueInstant=2013-08-12T23%3A29%3A10Z&ProviderID=https%3A%2F%2Fag2e2ssl.dmp.wa.gov.au%3A443%2Fnesp%2Fidff%2Fmetadata&RelayState=Mg%3D%3D&consent=urn%3Aliberty%3Aconsent%3Aunavailable&ForceAuthn=false&IsPassive=false&NameIDPolicy=onetime&ProtocolProfile=http%3A%2F%2Fprojectliberty.org%2Fprofiles%2Fbrws-art&target=https%3A%2F%2Face.dmp.wa.gov.au%2FACE%2FSecurity%2FLogin%3FReturnUrl%3D%252face%252f&AuthnContextStatementRef=name%2Fpassword%2Furi
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/idff/sso?id=3&sid=0&option=credential&sid=0
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RefreshAndMapBrowsersAndFrames() : Calling RefreshDomTree
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Setting IsDomLoaded=true
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Invoking (Propagating the DocumentComplete event)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : EnableSurface
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ClearHighlights
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : If DomVisible Populate it
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : DOM is NOT Visible
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : RequestMatch called
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling InitializeSilverlightRecorder()
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : DesignerBrowser is Ready. Attaching Events
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling AttachRecordingListener
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : Inside the (lock)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Releasing HtmlDoc References (Count:3)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Creating the (MAIN) document reference.
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RebuildDocReferences() : Building (FRAMES) and references.
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/jsp/content.jsp?sid=0&id=3&sid=0&RequestID=idsujUcgt.00zr360e3upQlo5tDOc&MajorVersion=1&MinorVersion=2&IssueInstant=2013-08-12T23%3A29%3A10Z&ProviderID=https%3A%2F%2Fag2e2ssl.dmp.wa.gov.au%3A443%2Fnesp%2Fidff%2Fmetadata&RelayState=Mg%3D%3D&consent=urn%3Aliberty%3Aconsent%3Aunavailable&ForceAuthn=false&IsPassive=false&NameIDPolicy=onetime&ProtocolProfile=http%3A%2F%2Fprojectliberty.org%2Fprofiles%2Fbrws-art&target=https%3A%2F%2Face.dmp.wa.gov.au%2FACE%2FSecurity%2FLogin%3FReturnUrl%3D%252face%252f&AuthnContextStatementRef=name%2Fpassword%2Furi
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.BuildFrames() : IERecordingSurface.BuildFrames create reference for : https://is2e1.dmp.wa.gov.au/nidp/idff/sso?id=3&sid=0&option=credential&sid=0
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.AttachRecordingListener() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.RefreshAndMapBrowsersAndFrames() : Calling RefreshDomTree
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Setting IsDomLoaded=true
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Invoking (Propagating the DocumentComplete event)
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : EnableSurface
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ClearHighlights
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : If DomVisible Populate it
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : DOM is NOT Visible
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : RequestMatch called
[08/13 12:32:42,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_DocumentCompleted() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : Calling InitializeSilverlightRecorder()
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function Start -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] SilverlightRecorderManager.InitializeRecorders() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeSilverlightRecorder() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.InitializeDocument() : ------- Function End -------
[08/13 12:32:42,iexplore.exe(4592:1),Recording] IERecordingSurface.IEBrowser_DocumentComplete() : ------- Function End -------
[08/13 12:33:01,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : (IERecordingSurface.ProcessClick) Processing an Html Click event
[08/13 12:33:01,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Retrieving IHtmlElement from Point
[08/13 12:33:01,iexplore.exe(4592:1),Uncategorized] IERecordingSurface.ProcessClick() : ElementProxy from GetElementProxyFromIHtmlElement is not null
[08/13 12:33:01,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Element clicked tag : INPUT
[08/13 12:33:05,iexplore.exe(4592:17)] First trace message from pool unnamed thread (managed ID = 17, native ID = 2348).
[08/13 12:33:05,iexplore.exe(4592:17),Recording] WebRecordingSurfaceManager._recorder_SetText() : Translate -> _recorder.SetTextClick
[08/13 12:33:05,iexplore.exe(4592:17),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function Start -------
[08/13 12:33:05,iexplore.exe(4592:17),Recording] WebRecordingSurfaceManager.PreRecordDescriptors() : Transitioning to ReadyToEdit state
[08/13 12:33:05,iexplore.exe(4592:17),Recording] ElementsGenerator.CreateHtmlElementDescriptor() : Generated Html FindExpr : name=Ecom_User_ID,tagname=input 
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:06,iexplore.exe(4592:17),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function End -------
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:06,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:08,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : (IERecordingSurface.ProcessClick) Processing an Html Click event
[08/13 12:33:08,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Retrieving IHtmlElement from Point
[08/13 12:33:08,iexplore.exe(4592:1),Uncategorized] IERecordingSurface.ProcessClick() : ElementProxy from GetElementProxyFromIHtmlElement is not null
[08/13 12:33:08,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Element clicked tag : INPUT
[08/13 12:33:11,iexplore.exe(4592:16)] First trace message from pool unnamed thread (managed ID = 16, native ID = 6180).
[08/13 12:33:11,iexplore.exe(4592:16),Recording] WebRecordingSurfaceManager._recorder_SetText() : Translate -> _recorder.SetTextClick
[08/13 12:33:11,iexplore.exe(4592:16),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function Start -------
[08/13 12:33:11,iexplore.exe(4592:16),Recording] WebRecordingSurfaceManager.PreRecordDescriptors() : Transitioning to ReadyToEdit state
[08/13 12:33:11,iexplore.exe(4592:16),Recording] ElementsGenerator.CreateHtmlElementDescriptor() : Generated Html FindExpr : name=Ecom_Password,tagname=input 
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:11,iexplore.exe(4592:16),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function End -------
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:11,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:12,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : (IERecordingSurface.ProcessClick) Processing an Html Click event
[08/13 12:33:12,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Retrieving IHtmlElement from Point
[08/13 12:33:12,iexplore.exe(4592:1),Uncategorized] IERecordingSurface.ProcessClick() : ElementProxy from GetElementProxyFromIHtmlElement is not null
[08/13 12:33:12,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Element clicked tag : TD
[08/13 12:33:12,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Click() : Translate -> _recorder.Click
[08/13 12:33:12,iexplore.exe(4592:1),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function Start -------
[08/13 12:33:12,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager.PreRecordDescriptors() : Transitioning to ReadyToEdit state
[08/13 12:33:12,iexplore.exe(4592:1),Recording] ElementsGenerator.CreateHtmlElementDescriptor() : Generated Html FindExpr : TagIndex=td:5 
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:12,iexplore.exe(4592:1),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function End -------
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:12,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:28,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : (IERecordingSurface.ProcessClick) Processing an Html Click event
[08/13 12:33:28,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Retrieving IHtmlElement from Point
[08/13 12:33:28,iexplore.exe(4592:1),Uncategorized] IERecordingSurface.ProcessClick() : ElementProxy from GetElementProxyFromIHtmlElement is not null
[08/13 12:33:28,iexplore.exe(4592:1),Recording] IERecordingSurface.ProcessClick() : Element clicked tag : TD
[08/13 12:33:28,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager._recorder_Click() : Translate -> _recorder.Click
[08/13 12:33:28,iexplore.exe(4592:1),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function Start -------
[08/13 12:33:28,iexplore.exe(4592:1),Recording] WebRecordingSurfaceManager.PreRecordDescriptors() : Transitioning to ReadyToEdit state
[08/13 12:33:28,iexplore.exe(4592:1),Recording] ElementsGenerator.CreateHtmlElementDescriptor() : Generated Html FindExpr : TagIndex=td:4 
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:28,iexplore.exe(4592:1),Recording] RecordingSurfaceManagerBase.RecordDescriptorsInProject() : ------- Function End -------
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:28,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:32,iexplore.exe(4592:1),Recording] RemoteRecorder._ie_OnQuit() : Unbinding WebRecordingSurfaceManager...
[08/13 12:33:32,iexplore.exe(4592:1),Recording] RemoteRecorder._ie_OnQuit() : Removing HWND 984720
[08/13 12:33:32,iexplore.exe(4592:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_c0d05290-5238-4f9f-979c-4b31375c54d1") to pipe server...
[08/13 12:33:32,Telerik.TestStudio.exe(1460:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A ClientDisconnectRequest(ClientId="Client_c0d05290-5238-4f9f-979c-4b31375c54d1") has been received from the pipe client.
[08/13 12:33:32,Telerik.TestStudio.exe(1460:18),Framework] Manager.RemoveBrowser() : Removed client ID "Client_c0d05290-5238-4f9f-979c-4b31375c54d1" (0 remaining).
[08/13 12:33:32,iexplore.exe(4592:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[08/13 12:33:32,Telerik.TestStudio.exe(1460:18),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[08/13 12:33:32,Telerik.TestStudio.exe(1460:18),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 18).
[08/13 12:33:41,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function Start -------
[08/13 12:33:41,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : Project is offline or uncontrolled; making files writeable
[08/13 12:33:41,Telerik.TestStudio.exe(1460:1),ProjectModel] StandaloneHost.EditControlledFiles() : ------- Function End -------
[08/13 12:33:42,ArtOfTest.Runner.exe(6964:3)] First trace message from process 6964: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe" /controller /parentprocesshandle=4972
[08/13 12:33:42,ArtOfTest.Runner.exe(6964:3)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 3, native ID = 5428).
[08/13 12:33:42,ArtOfTest.Runner.exe(6964:3),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[08/13 12:33:42,ArtOfTest.Runner.exe(6964:3),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[08/13 12:33:43,ArtOfTest.Runner.exe(6964:3),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6)] First trace message from pool unnamed thread (managed ID = 6, native ID = 5232).
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=7016, Path="C:\Program Files (x86)\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=198346)...
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] Connector.Start() : Process launched (ID=6636, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 263840").
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] Connector.Start() : Process exited (ID=6636, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 263840").
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio" (ID=1460) is assumed to host the controller.
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] Connector.InjectCode() : ------- Function Start -------
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] Connector.InjectCode() : Connection string: C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.2.1527.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?1460
[08/13 12:33:44,ArtOfTest.Runner.exe(6964:6),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 263840 on another thread...
[08/13 12:33:45,ArtOfTest.Runner.exe(6964:5)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 5, native ID = 4724).
[08/13 12:33:45,ArtOfTest.Runner.exe(6964:5),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[08/13 12:33:45,ArtOfTest.Runner.exe(6964:6),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:33:45,ArtOfTest.Runner.exe(6964:6),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 263840 (lpData = "C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.2.1527.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?1460")...
[08/13 12:34:10,iexplore.exe(2196:1)] First trace message from process 2196: "C:\Program Files (x86)\Internet Explorer\iexplore.exe" SCODEF:7016 CREDAT:145409
[08/13 12:34:10,iexplore.exe(2196:1)] First trace message from background thread "ArtOfTestPluginEntryPoint entry point thread" (managed ID = 1, native ID = 3308).
[08/13 12:34:10,iexplore.exe(2196:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 263840, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-232033958", PID = 1460).
[08/13 12:34:10,iexplore.exe(2196:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 263840 on same thread...
[08/13 12:34:10,iexplore.exe(2196:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[08/13 12:34:10,iexplore.exe(2196:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_8beb9139-852b-42de-99ec-ad0eba6d74e8".
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:9)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 9, native ID = 1312).
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:9),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:13)] First trace message from background thread "Remoted async command listener" (managed ID = 13, native ID = 324).
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[08/13 12:34:10,iexplore.exe(2196:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "5dfc0361-5c42-4360-8231-50b31ad1de29.CommandPipe", Async = "5dfc0361-5c42-4360-8231-50b31ad1de29.AsyncPipe"}
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:6),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:9),Framework] Manager.AddNewBrowser() : Added client ID "Client_8beb9139-852b-42de-99ec-ad0eba6d74e8" (now there is/are 1 total).
[08/13 12:34:10,ArtOfTest.Runner.exe(6964:6),Framework] Connector.InjectCode() : ------- Function End -------
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Got 6 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Load.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Manual.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Web.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Wpf.dll" from plugins folder.
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[08/13 12:34:11,ArtOfTest.Runner.exe(6964:6),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:7)] First trace message from foreground thread "UAI Dispatcher Thread" (managed ID = 7, native ID = 6136).
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:7),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[08/13 12:34:12,ArtOfTest.Runner.exe(6964:7),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Error] ExecutionEngine.ExecuteStep() : EXCEPTION! (see below)
     Outer Exception Type: System.Exception
     Message: Unable to find the target host (Browser/SilverlightApp) to locate an element. Failure: Waiting for frame '[Frame:id=credentials,name=Frame_1,src=https://is2e1.dmp.wa.gov.au/nidp/idff/sso,UseQuery:False]' timed out. Error: Wait for condition has timed out
     HRESULT: 0x80131500 (Official ID (if app.) = COR_E_EXCEPTION, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5376)
     Call Stack:
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.WaitForAllElements(IAutomationHost host, AutomationDescriptor descriptor, Int32 timeout)
          at ArtOfTest.WebAii.Design.Execution.ExecutionEngine.ExecuteStep(Int32 order)

[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::BreakOnFail
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::ShutDown::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::End
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DispatcherBeginInvokeShutdown::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::Close::Start
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-232033958" in order to unblock and eventually terminate it...
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:9),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] Manager.RemoveBrowser() : Removed client ID "Client_8beb9139-852b-42de-99ec-ad0eba6d74e8" (0 remaining).
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:6),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 13).
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:7),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[08/13 12:35:13,ArtOfTest.Runner.exe(6964:13),Warning] PipeCommunication.AsyncPipeRead() : Pipe read wait broken by thread-abort.
[08/13 12:35:14,ArtOfTest.Runner.exe(6964:6),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[08/13 12:35:15,Telerik.TestStudio.exe(1460:71)] First trace message from background thread "Callback Listener Thread" (managed ID = 71, native ID = 6696).
[08/13 12:35:15,Telerik.TestStudio.exe(1460:71),Warning] PipeCommunication.AsyncPipeRead() : Pipe was already disposed at the moment of the wait attempt.
